[INFO] fetching crate minijinja 2.18.0...
[INFO] testing minijinja-2.18.0 against try#0abe69e6c16114311cc2700e972492e64d69c28f for pr-154065-1
[INFO] extracting crate minijinja 2.18.0 into /workspace/builds/worker-7-tc2/source
[INFO] started tweaking crates.io crate minijinja 2.18.0
[INFO] finished tweaking crates.io crate minijinja 2.18.0
[INFO] tweaked toml for crates.io crate minijinja 2.18.0 written to /workspace/builds/worker-7-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate minijinja 2.18.0 on toolchain 0abe69e6c16114311cc2700e972492e64d69c28f
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+0abe69e6c16114311cc2700e972492e64d69c28f" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate minijinja 2.18.0 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+0abe69e6c16114311cc2700e972492e64d69c28f" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+0abe69e6c16114311cc2700e972492e64d69c28f" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 0af6992c14feced559d196cd40edb34bb3c63e057cf85c59c831259e5aa9a818
[INFO] running `Command { std: "docker" "start" "-a" "0af6992c14feced559d196cd40edb34bb3c63e057cf85c59c831259e5aa9a818", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "0af6992c14feced559d196cd40edb34bb3c63e057cf85c59c831259e5aa9a818", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "0af6992c14feced559d196cd40edb34bb3c63e057cf85c59c831259e5aa9a818", kill_on_drop: false }`
[INFO] [stdout] 0af6992c14feced559d196cd40edb34bb3c63e057cf85c59c831259e5aa9a818
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+0abe69e6c16114311cc2700e972492e64d69c28f" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] bfc5fd1ae5c1d9df0889d9e7f599072ce68b029db5dbfc564ebb51a598b31d13
[INFO] running `Command { std: "docker" "start" "-a" "bfc5fd1ae5c1d9df0889d9e7f599072ce68b029db5dbfc564ebb51a598b31d13", kill_on_drop: false }`
[INFO] [stderr]    Compiling serde v1.0.219
[INFO] [stderr]    Compiling memo-map v0.3.3
[INFO] [stderr]    Compiling minijinja v2.18.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 9.86s
[INFO] running `Command { std: "docker" "inspect" "bfc5fd1ae5c1d9df0889d9e7f599072ce68b029db5dbfc564ebb51a598b31d13", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "bfc5fd1ae5c1d9df0889d9e7f599072ce68b029db5dbfc564ebb51a598b31d13", kill_on_drop: false }`
[INFO] [stdout] bfc5fd1ae5c1d9df0889d9e7f599072ce68b029db5dbfc564ebb51a598b31d13
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+0abe69e6c16114311cc2700e972492e64d69c28f" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 09cff6280c1784ebc43bfa46dcca6ab3506249b90a0356b4e3de4c3fc2f59c51
[INFO] running `Command { std: "docker" "start" "-a" "09cff6280c1784ebc43bfa46dcca6ab3506249b90a0356b4e3de4c3fc2f59c51", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.95
[INFO] [stderr]    Compiling memchr v2.7.4
[INFO] [stderr]    Compiling libc v0.2.172
[INFO] [stderr]    Compiling regex-syntax v0.8.5
[INFO] [stderr]    Compiling unicode-segmentation v1.12.0
[INFO] [stderr]    Compiling log v0.4.27
[INFO] [stderr]    Compiling similar v2.7.0
[INFO] [stderr]    Compiling aho-corasick v1.1.3
[INFO] [stderr]    Compiling bstr v1.12.0
[INFO] [stderr]    Compiling quote v1.0.40
[INFO] [stderr]    Compiling syn v2.0.101
[INFO] [stderr]    Compiling console v0.15.11
[INFO] [stderr]    Compiling similar-asserts v1.7.0
[INFO] [stderr]    Compiling regex-automata v0.4.9
[INFO] [stderr]    Compiling serde_derive v1.0.219
[INFO] [stderr]    Compiling globset v0.4.16
[INFO] [stderr]    Compiling serde v1.0.219
[INFO] [stderr]    Compiling insta v1.43.1
[INFO] [stderr]    Compiling serde_json v1.0.140
[INFO] [stderr]    Compiling minijinja v2.18.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 25.03s
[INFO] running `Command { std: "docker" "inspect" "09cff6280c1784ebc43bfa46dcca6ab3506249b90a0356b4e3de4c3fc2f59c51", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "09cff6280c1784ebc43bfa46dcca6ab3506249b90a0356b4e3de4c3fc2f59c51", kill_on_drop: false }`
[INFO] [stdout] 09cff6280c1784ebc43bfa46dcca6ab3506249b90a0356b4e3de4c3fc2f59c51
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+0abe69e6c16114311cc2700e972492e64d69c28f" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 544eb0d504997128a08b31e3b63c26e1c9ae122101c0f04849735ea55fb23618
[INFO] running `Command { std: "docker" "start" "-a" "544eb0d504997128a08b31e3b63c26e1c9ae122101c0f04849735ea55fb23618", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.05s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/minijinja-e53b538c404ebaa1)
[INFO] [stdout] 
[INFO] [stdout] running 26 tests
[INFO] [stdout] test compiler::instructions::test_sizes ... ok
[INFO] [stdout] test compiler::lexer::tests::test_is_basic_tag ... ok
[INFO] [stdout] test defaults::unit_tests::test_default_uto_escape ... ok
[INFO] [stdout] test loader::tests::test_safe_join ... ok
[INFO] [stdout] test utils::tests::test_small_u64_format_large_values_are_not_cached ... ok
[INFO] [stdout] test utils::tests::test_small_u64_format_cache_bounds ... ok
[INFO] [stdout] test utils::tests::test_splitn_whitespace ... ok
[INFO] [stdout] test utils::tests::test_unescape ... ok
[INFO] [stdout] test value::argtypes::tests::test_as_f64 ... ok
[INFO] [stdout] test compiler::lexer::tests::test_basic_identifiers ... ok
[INFO] [stdout] test value::argtypes::tests::test_kwargs_fails_string_conversion ... ok
[INFO] [stdout] test value::argtypes::tests::test_optional_none ... ok
[INFO] [stdout] test value::argtypes::tests::test_split_kwargs ... ok
[INFO] [stdout] test value::merge_object::test_merge_object ... ok
[INFO] [stdout] test value::ops::tests::test_bytes_slicing ... ok
[INFO] [stdout] test value::ops::tests::test_concat ... ok
[INFO] [stdout] test value::ops::tests::test_neg ... ok
[INFO] [stdout] test value::ops::tests::test_slicing ... ok
[INFO] [stdout] test value::ops::tests::test_string_slicing ... ok
[INFO] [stdout] test value::ops::tests::test_subtracting ... ok
[INFO] [stdout] test value::ops::tests::test_dividing ... ok
[INFO] [stdout] test value::ops::tests::test_adding ... ok
[INFO] [stdout] test value::tests::test_dynamic_object_roundtrip ... ok
[INFO] [stdout] test value::tests::test_string_char ... ok
[INFO] [stdout] test value::tests::test_sizes ... ok
[INFO] [stdout] test utils::tests::test_html_escape ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 26 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.07s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests minijinja
[INFO] [stdout] 
[INFO] [stdout] running 93 tests
[INFO] [stdout] test src/environment.rs - environment::Environment<'source>::add_template_owned (line 189) ... ok
[INFO] [stdout] test src/environment.rs - environment::Environment<'source>::set_loader (line 220) ... ok
[INFO] [stdout] test src/environment.rs - environment::Environment<'source>::set_path_join_callback (line 304) ... ok
[INFO] [stdout] test src/error.rs - error::Error (line 22) ... ok
[INFO] [stdout] test src/environment.rs - environment::Environment<'source>::set_auto_escape_callback (line 497) ... ok
[INFO] [stdout] test src/environment.rs - environment::Environment<'source>::set_formatter (line 548) ... ok
[INFO] [stdout] test src/filters.rs - filters (line 55) ... ok
[INFO] [stdout] test src/environment.rs - environment::Environment<'source>::set_unknown_method_callback (line 333) ... ok
[INFO] [stdout] test src/environment.rs - environment::Environment<'source>::add_template (line 169) ... ok
[INFO] [stdout] test src/expression.rs - expression::Expression (line 29) ... ok
[INFO] [stdout] test src/environment.rs - environment::Environment<'source>::get_template (line 397) ... ok
[INFO] [stdout] test src/filters.rs - filters (line 35) ... ok
[INFO] [stdout] test src/environment.rs - environment::Environment<'source>::template_from_named_str (line 413) ... ok
[INFO] [stdout] test src/error.rs - error::Error::range (line 293) ... ok
[INFO] [stdout] test src/filters.rs - filters (line 75) ... ok
[INFO] [stdout] test src/filters.rs - filters (line 97) ... ok
[INFO] [stdout] test src/functions.rs - functions::Function (line 185) ... ok
[INFO] [stdout] test src/functions.rs - functions (line 51) ... ok
[INFO] [stdout] test src/loader.rs - loader::path_loader (line 199) ... ok
[INFO] [stdout] test src/environment.rs - environment::Environment<'source>::templates (line 372) ... ok
[INFO] [stdout] test src/functions.rs - functions (line 27) ... ok
[INFO] [stdout] test src/lib.rs - (line 43) ... ok
[INFO] [stdout] test src/environment.rs - environment::Environment<'source>::render_named_str (line 450) ... ok
[INFO] [stdout] test src/template.rs - template::Template<'env,'source>::eval_to_state (line 358) ... ok
[INFO] [stdout] test src/functions.rs - functions::Function (line 145) ... ok
[INFO] [stdout] test src/macros.rs - macros::context (line 56) ... ok
[INFO] [stdout] test src/lib.rs - (line 67) ... ok
[INFO] [stdout] test src/functions.rs - functions::Function (line 167) ... ok
[INFO] [stdout] test src/macros.rs - macros::args (line 201) ... ok
[INFO] [stdout] test src/macros.rs - macros::context (line 95) ... ok
[INFO] [stdout] test src/macros.rs - macros::context (line 78) ... ok
[INFO] [stdout] test src/macros.rs - macros::render (line 292) ... ok
[INFO] [stdout] test src/template.rs - template::Template<'env,'source>::render_captured (line 228) ... ok
[INFO] [stdout] test src/template.rs - template::Template<'env,'source>::undeclared_variables (line 411) ... ok
[INFO] [stdout] test src/template.rs - template::Template<'env,'source>::render_and_return_state (line 200) ... ok
[INFO] [stdout] test src/tests.rs - tests (line 36) ... ok
[INFO] [stdout] test src/lib.rs - (line 85) ... ok
[INFO] [stdout] test src/value/argtypes.rs - value::argtypes::Kwargs (line 760) ... ok
[INFO] [stdout] test src/value/argtypes.rs - value::argtypes::Kwargs::get (line 874) ... ok
[INFO] [stdout] test src/value/argtypes.rs - value::argtypes::Kwargs (line 724) ... ok
[INFO] [stdout] test src/template.rs - template::Template<'env,'source>::render_to_write (line 327) ... ok
[INFO] [stdout] test src/template.rs - template::Template<'env,'source>::render_captured_to (line 252) ... ok
[INFO] [stdout] test src/macros.rs - macros::render (line 285) ... ok
[INFO] [stdout] test src/value/argtypes.rs - value::argtypes::Kwargs (line 747) ... ok
[INFO] [stdout] test src/template.rs - template::Template<'env,'source>::render (line 175) ... ok
[INFO] [stdout] test src/value/argtypes.rs - value::argtypes::from_args (line 64) ... ok
[INFO] [stdout] test src/macros.rs - macros::context (line 67) ... ok
[INFO] [stdout] test src/value/mod.rs - value (line 159) ... ok
[INFO] [stdout] test src/value/deserialize.rs - value::deserialize::ViaDeserialize (line 97) ... ok
[INFO] [stdout] test src/value/mod.rs - value (line 47) ... ok
[INFO] [stdout] test src/value/argtypes.rs - value::argtypes::from_args (line 79) ... ok
[INFO] [stdout] test src/value/argtypes.rs - value::argtypes::Rest (line 661) ... ok
[INFO] [stdout] test src/macros.rs - macros::render (line 300) ... ok
[INFO] [stdout] test src/value/mod.rs - value (line 16) ... ok
[INFO] [stdout] test src/value/mod.rs - value (line 55) ... ok
[INFO] [stdout] test src/value/mod.rs - value (line 137) ... ok
[INFO] [stdout] test src/value/mod.rs - value (line 91) ... ok
[INFO] [stdout] test src/value/mod.rs - value (line 33) ... ok
[INFO] [stdout] test src/value/mod.rs - value (line 100) ... ok
[INFO] [stdout] test src/value/merge_object.rs - value::merge_object::merge_maps (line 110) ... ok
[INFO] [stdout] test src/value/mod.rs - value::Value::get_item_by_index (line 1323) ... ok
[INFO] [stdout] test src/value/mod.rs - value::Value::from_dyn_object (line 858) ... ok
[INFO] [stdout] test src/value/mod.rs - value::Value::from_function (line 1095) ... ok
[INFO] [stdout] test src/value/mod.rs - value::Value::get_attr (line 1286) ... ok
[INFO] [stdout] test src/value/mod.rs - value (line 75) ... ok
[INFO] [stdout] test src/value/mod.rs - value::Value::from_serialize (line 759) ... ok
[INFO] [stdout] test src/value/mod.rs - value::Value::from_safe_string (line 809) ... ok
[INFO] [stdout] test src/value/mod.rs - value::Value::call (line 1579) ... ok
[INFO] [stdout] test src/value/object.rs - value::object::Enumerator::Iter (line 541) ... ok
[INFO] [stdout] test src/value/mod.rs - value::Value::len (line 1265) ... ok
[INFO] [stdout] test src/value/mod.rs - value::Value::make_iterable (line 906) ... ok
[INFO] [stdout] test src/vendor/self_cell/mod.rs - vendor::self_cell::self_cell (line 20) ... ignored
[INFO] [stdout] test src/value/mod.rs - value::Value::from_object (line 835) ... ok
[INFO] [stdout] test src/value/mod.rs - value::Value::get_item (line 1340) ... ok
[INFO] [stdout] test src/value/mod.rs - value::Value::call (line 1601) ... ok
[INFO] [stdout] test src/value/mod.rs - value::Value::downcast_object_ref (line 1485) ... ok
[INFO] [stdout] test src/value/mod.rs - value::Value::make_one_shot_iterator (line 1075) ... ok
[INFO] [stdout] test src/value/mod.rs - value::Value::make_object_map (line 985) ... ok
[INFO] [stdout] test src/value/object.rs - value::object::ObjectExt::mapped_enumerator (line 382) ... ok
[INFO] [stdout] test src/value/mod.rs - value::Value::try_iter (line 1366) ... ok
[INFO] [stdout] test src/value/object.rs - value::object::ObjectExt::mapped_rev_enumerator (line 422) ... ok
[INFO] [stdout] test src/vm/state.rs - vm::state::State<'template,'env>::get_or_set_temp_object (line 378) ... ok
[INFO] [stdout] test src/value/object.rs - value::object::Object::custom_cmp (line 274) ... ok
[INFO] [stdout] test src/value/object.rs - value::object::Object (line 26) ... ok
[INFO] [stdout] test src/vm/state.rs - vm::state::State<'template,'env>::get_temp (line 345) ... ok
[INFO] [stdout] test src/value/object.rs - value::object::Object (line 60) ... ok
[INFO] [stdout] test src/vm/state.rs - vm::state::State<'template,'env>::apply_filter (line 266) ... ok
[INFO] [stdout] test src/vm/state.rs - vm::state::State<'template,'env>::perform_test (line 284) ... ok
[INFO] [stdout] test src/vm/state.rs - vm::state::State<'template,'env>::render_block (line 192) ... ok
[INFO] [stdout] test src/value/mod.rs - value::Value::make_object_iterable (line 930) ... ok
[INFO] [stdout] test src/value/object.rs - value::object::Object (line 96) ... ok
[INFO] [stdout] test src/vm/state.rs - vm::state::State<'template,'env>::format (line 302) ... ok
[INFO] [stdout] test src/value/object.rs - value::object::Object (line 134) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 92 passed; 0 failed; 1 ignored; 0 measured; 0 filtered out; finished in 8.49s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "544eb0d504997128a08b31e3b63c26e1c9ae122101c0f04849735ea55fb23618", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "544eb0d504997128a08b31e3b63c26e1c9ae122101c0f04849735ea55fb23618", kill_on_drop: false }`
[INFO] [stdout] 544eb0d504997128a08b31e3b63c26e1c9ae122101c0f04849735ea55fb23618
